Dec 02 16:11:29.098 INFO testing solana_rbpf-0.1.4 against master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61 for beta-1.31-5
Dec 02 16:11:29.098 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 16:11:29.296 INFO [stdout] 70b686eb68f456b762009ec3c32513ceacf593f7d6a3b1f3daf9933ed002b1d9
Dec 02 16:11:29.298 INFO running `"docker" "start" "-a" "70b686eb68f456b762009ec3c32513ceacf593f7d6a3b1f3daf9933ed002b1d9"`
Dec 02 16:11:29.770 INFO [stderr] usermod: no changes
Dec 02 16:11:29.958 INFO [stderr]    Compiling ar v0.6.1
Dec 02 16:11:29.958 INFO [stderr]    Compiling bloom v0.3.2
Dec 02 16:11:29.958 INFO [stderr]    Compiling combine v2.5.2
Dec 02 16:11:29.967 INFO [stderr]    Compiling pretty_env_logger v0.2.5
Dec 02 16:11:34.150 INFO [stderr]    Compiling elfkit v0.0.6
Dec 02 16:11:44.099 INFO [stderr]    Compiling solana_rbpf v0.1.4 (/source)
Dec 02 16:11:49.615 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.83s
Dec 02 16:11:49.625 INFO [stderr] su: No module specific data is present
Dec 02 16:11:50.024 INFO running `"docker" "inspect" "70b686eb68f456b762009ec3c32513ceacf593f7d6a3b1f3daf9933ed002b1d9"`
Dec 02 16:11:50.276 INFO running `"docker" "rm" "-f" "70b686eb68f456b762009ec3c32513ceacf593f7d6a3b1f3daf9933ed002b1d9"`
Dec 02 16:11:50.521 INFO [stdout] 70b686eb68f456b762009ec3c32513ceacf593f7d6a3b1f3daf9933ed002b1d9
Dec 02 16:11:50.531 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 16:11:50.860 INFO [stdout] 5d55eff649cffa43b143d009f86c3552fbdc8c0764d5640d2c53f654fd9a11f3
Dec 02 16:11:50.864 INFO running `"docker" "start" "-a" "5d55eff649cffa43b143d009f86c3552fbdc8c0764d5640d2c53f654fd9a11f3"`
Dec 02 16:11:51.415 INFO [stderr] usermod: no changes
Dec 02 16:11:51.591 INFO [stderr]    Compiling solana_rbpf v0.1.4 (/source)
Dec 02 16:12:16.734 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 25.30s
Dec 02 16:12:16.748 INFO [stderr] su: No module specific data is present
Dec 02 16:12:17.591 INFO running `"docker" "inspect" "5d55eff649cffa43b143d009f86c3552fbdc8c0764d5640d2c53f654fd9a11f3"`
Dec 02 16:12:17.955 INFO running `"docker" "rm" "-f" "5d55eff649cffa43b143d009f86c3552fbdc8c0764d5640d2c53f654fd9a11f3"`
Dec 02 16:12:18.254 INFO [stdout] 5d55eff649cffa43b143d009f86c3552fbdc8c0764d5640d2c53f654fd9a11f3
Dec 02 16:12:18.263 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 16:12:18.663 INFO [stdout] bdf623c5cc8d8365b6e03bd6d770a93bd213f706f039a2875d989b466a6939d0
Dec 02 16:12:18.663 INFO running `"docker" "start" "-a" "bdf623c5cc8d8365b6e03bd6d770a93bd213f706f039a2875d989b466a6939d0"`
Dec 02 16:12:19.915 INFO [stderr] usermod: no changes
Dec 02 16:12:20.223 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.26s
Dec 02 16:12:20.243 INFO [stderr]      Running /target/debug/deps/solana_rbpf-4ecef72d77416d46
Dec 02 16:12:20.250 INFO [stdout] 
Dec 02 16:12:20.250 INFO [stdout] running 119 tests
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_error_eof ... ok
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_empty ... ok
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_ident ... ok
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_exit ... ok
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_initial_whitespace ... ok
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_error_unexpected_character ... ok
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_instruction ... ok
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_integer ... ok
Dec 02 16:12:20.263 INFO [stdout] test elf::test::test_validate ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_big_endian_16bits ... ok
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_ldxh ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_big_endian_32bits ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_big_endian_64bit ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_little_endian_16bits ... ok
Dec 02 16:12:20.263 INFO [stdout] test asm_parser::tests::test_ja ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_little_endian_32bits ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_little_endian_64bit ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_bit_and_with_const_not_equal_zero ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_equals_const ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_or_equals_src_signed ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_or_equals_to_const ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_than_const ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_than_const_signed ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_or_equals_src_signed ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_or_equals_to_const ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_than_const ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_than_const_signed ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_not_equals_const ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_to_label ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_bit_and_with_src_not_equal_zero ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_equals_src ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_or_equals_src_signed ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_or_equals_to_src ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_than_src ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_than_src_signed ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_or_equals_src_signed ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_or_equals_to_src ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_than_src ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_than_src_signed ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_not_equals_src ... ok
Dec 02 16:12:20.263 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_byte ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_double_word ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_half_word ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_word ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_double_word ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_byte ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_double_word ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_half_word ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_word ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::register::load_byte_from_set_src_with_offset ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::register::load_double_word_from_set_src_with_offset ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::register::load_half_word_from_set_src_with_offset ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::load_instructions::register::load_word_from_set_src_with_offset ... ok
Dec 02 16:12:20.264 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_and_add_const_to_register ... ok
Dec 02 16:12:20.271 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_bit_and_const_to_register ... ok
Dec 02 16:12:20.272 INFO [stdout] test asm_parser::tests::test_operand ... ok
Dec 02 16:12:20.272 INFO [stdout] test asm_parser::tests::test_register ... ok
Dec 02 16:12:20.275 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_bit_or_const_to_register ... ok
Dec 02 16:12:20.275 INFO [stdout] test asm_parser::tests::test_lsh ... ok
Dec 02 16:12:20.275 INFO [stdout] test asm_parser::tests::test_tcp_sack ... ok
Dec 02 16:12:20.284 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_left_shift_const_to_register ... ok
Dec 02 16:12:20.291 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_mod_const_to_register ... ok
Dec 02 16:12:20.291 INFO [stdout] test elf::test::test_relocate ... ok
Dec 02 16:12:20.291 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_const_to_register ... ok
Dec 02 16:12:20.291 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_div_constant_to_register ... ok
Dec 02 16:12:20.292 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_mul_const_to_register ... ok
Dec 02 16:12:20.292 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_logical_right_shift_const_to_register ... ok
Dec 02 16:12:20.292 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_bit_and_from_register_to_register ... ok
Dec 02 16:12:20.296 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_bit_xor_const_to_register ... ok
Dec 02 16:12:20.296 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_div_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_sub_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_negate_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_signed_right_shift_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_and_add_from_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_signed_right_shift_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_mul_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_bit_xor_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_mod_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_bit_or_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_sub_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_and_add_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_bit_and_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_bit_or_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_bit_xor_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_div_constant_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_left_shift_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_logical_right_shift_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_mod_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_mul_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_negate_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_signed_right_shift_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_sub_const_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_and_add_from_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_bit_and_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_bit_or_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_bit_xor_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_div_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_from_register_to_another_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_left_shift_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_logical_right_shift_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_mod_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_mul_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_signed_right_shift_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_sub_from_register_to_register ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::programs::example_from_assembler ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::special::call_immediate ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::special::exit_operation ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::store_instructions::store_byte_from_dst_into_immediate_address ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::store_instructions::store_byte_from_dst_into_src_address ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::store_instructions::store_double_word_from_dst_into_immediate_address ... ok
Dec 02 16:12:20.297 INFO [stdout] test insn_builder::tests::store_instructions::store_double_word_from_dst_into_src_address ... ok
Dec 02 16:12:20.298 INFO [stdout] test insn_builder::tests::store_instructions::store_half_word_from_dst_into_immediate_address ... ok
Dec 02 16:12:20.298 INFO [stdout] test insn_builder::tests::store_instructions::store_half_word_from_dst_into_src_address ... ok
Dec 02 16:12:20.298 INFO [stdout] test insn_builder::tests::store_instructions::store_word_from_dst_into_immediate_address ... ok
Dec 02 16:12:20.298 INFO [stdout] test insn_builder::tests::store_instructions::store_word_from_dst_into_src_address ... ok
Dec 02 16:12:20.307 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_from_register_to_another_register ... ok
Dec 02 16:12:20.307 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_left_shift_from_register_to_register ... ok
Dec 02 16:12:20.312 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_logical_right_shift_from_register_to_register ... ok
Dec 02 16:12:20.312 INFO [stdout] 
Dec 02 16:12:20.312 INFO [stdout] test result: ok. 119 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 16:12:20.312 INFO [stdout] 
Dec 02 16:12:20.312 INFO [stdout] 
Dec 02 16:12:20.312 INFO [stdout] running 32 tests
Dec 02 16:12:20.312 INFO [stderr]      Running /target/debug/deps/assembler-4aea7508219847d5
Dec 02 16:12:20.315 INFO [stdout] test test_empty ... ok
Dec 02 16:12:20.315 INFO [stdout] test test_add64 ... ok
Dec 02 16:12:20.319 INFO [stdout] test test_call ... ok
Dec 02 16:12:20.319 INFO [stdout] test test_error_invalid_instruction ... ok
Dec 02 16:12:20.319 INFO [stdout] test test_endian ... ok
Dec 02 16:12:20.319 INFO [stdout] test test_be32 ... ok
Dec 02 16:12:20.319 INFO [stdout] test test_error_unexpected_operands ... ok
Dec 02 16:12:20.319 INFO [stdout] test test_exit ... ok
Dec 02 16:12:20.322 INFO [stdout] test test_ja ... ok
Dec 02 16:12:20.322 INFO [stdout] test test_alu_binary ... ok
Dec 02 16:12:20.322 INFO [stdout] test test_jeq ... ok
Dec 02 16:12:20.325 INFO [stdout] test test_error_too_many_operands ... ok
Dec 02 16:12:20.325 INFO [stdout] test test_alu_unary ... ok
Dec 02 16:12:20.325 INFO [stdout] test test_jump_conditional ... ok
Dec 02 16:12:20.325 INFO [stdout] test test_ldindw ... ok
Dec 02 16:12:20.325 INFO [stdout] test test_lddw ... ok
Dec 02 16:12:20.325 INFO [stdout] test test_error_operands_out_of_range ... ok
Dec 02 16:12:20.327 INFO [stdout] test test_ldabsw ... ok
Dec 02 16:12:20.327 INFO [stdout] test test_ldxw ... ok
Dec 02 16:12:20.327 INFO [stdout] test test_load_reg ... ok
Dec 02 16:12:20.327 INFO [stdout] test test_large_immediate ... ok
Dec 02 16:12:20.327 INFO [stdout] test test_neg64 ... ok
Dec 02 16:12:20.327 INFO [stdout] test test_ldxdw ... ok
Dec 02 16:12:20.329 INFO [stdout] test test_stxh ... ok
Dec 02 16:12:20.329 INFO [stdout] test test_stw ... ok
Dec 02 16:12:20.329 INFO [stdout] test test_stxw ... ok
Dec 02 16:12:20.329 INFO [stdout] test test_store_reg ... ok
Dec 02 16:12:20.329 INFO [stdout] test test_store_imm ... ok
Dec 02 16:12:20.330 INFO [stdout] test test_sth ... ok
Dec 02 16:12:20.330 INFO [stdout] test test_tcp_sack ... ok
Dec 02 16:12:20.343 INFO [stdout] test test_load_ind ... ok
Dec 02 16:12:20.351 INFO [stdout] test test_load_abs ... ok
Dec 02 16:12:20.351 INFO [stdout] 
Dec 02 16:12:20.351 INFO [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 16:12:20.351 INFO [stdout] 
Dec 02 16:12:20.351 INFO [stderr]      Running /target/debug/deps/common-abaff8185f08646f
Dec 02 16:12:20.357 INFO [stdout] 
Dec 02 16:12:20.357 INFO [stdout] running 0 tests
Dec 02 16:12:20.357 INFO [stdout] 
Dec 02 16:12:20.357 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 16:12:20.358 INFO [stdout] 
Dec 02 16:12:20.359 INFO [stderr]      Running /target/debug/deps/disassembler-3d5bc9647926963f
Dec 02 16:12:20.367 INFO [stdout] 
Dec 02 16:12:20.367 INFO [stdout] running 27 tests
Dec 02 16:12:20.367 INFO [stdout] test test_alu_unary ... ok
Dec 02 16:12:20.367 INFO [stdout] test test_empty ... ok
Dec 02 16:12:20.367 INFO [stdout] test test_be32 ... ok
Dec 02 16:12:20.370 INFO [stdout] test test_jeq ... ok
Dec 02 16:12:20.377 INFO [stdout] test test_alu_binary ... ok
Dec 02 16:12:20.377 INFO [stdout] test test_ja ... ok
Dec 02 16:12:20.383 INFO [stdout] test test_jump_conditional ... ok
Dec 02 16:12:20.383 INFO [stdout] test test_call ... ok
Dec 02 16:12:20.383 INFO [stdout] test test_add64 ... ok
Dec 02 16:12:20.383 INFO [stdout] test test_endian ... ok
Dec 02 16:12:20.383 INFO [stdout] test test_exit ... ok
Dec 02 16:12:20.395 INFO [stdout] test test_large_immediate ... ok
Dec 02 16:12:20.395 INFO [stdout] test test_load_abs ... ok
Dec 02 16:12:20.395 INFO [stdout] test test_ldxw ... ok
Dec 02 16:12:20.395 INFO [stdout] test test_ldindw ... ok
Dec 02 16:12:20.395 INFO [stdout] test test_ldxdw ... ok
Dec 02 16:12:20.395 INFO [stdout] test test_load_ind ... ok
Dec 02 16:12:20.395 INFO [stdout] test test_ldabsw ... ok
Dec 02 16:12:20.395 INFO [stdout] test test_lddw ... ok
Dec 02 16:12:20.403 INFO [stdout] test test_sth ... ok
Dec 02 16:12:20.404 INFO [stdout] test test_store_imm ... ok
Dec 02 16:12:20.406 INFO [stdout] test test_stxh ... ok
Dec 02 16:12:20.407 INFO [stdout] test test_neg64 ... ok
Dec 02 16:12:20.407 INFO [stdout] test test_stxw ... ok
Dec 02 16:12:20.407 INFO [stdout] test test_stw ... ok
Dec 02 16:12:20.432 INFO [stdout] test test_store_reg ... ok
Dec 02 16:12:20.432 INFO [stdout] test test_load_reg ... ok
Dec 02 16:12:20.432 INFO [stdout] 
Dec 02 16:12:20.432 INFO [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 16:12:20.432 INFO [stdout] 
Dec 02 16:12:20.436 INFO [stderr]      Running /target/debug/deps/misc-ceecc8b10d100774
Dec 02 16:12:20.437 INFO [stdout] 
Dec 02 16:12:20.437 INFO [stdout] running 30 tests
Dec 02 16:12:20.442 INFO [stdout] test test_jit_block_port ... ok
Dec 02 16:12:20.456 INFO [stdout] test test_jit_mbuff ... ok
Dec 02 16:12:20.463 INFO [stdout] test test_non_terminate_capped ... ok
Dec 02 16:12:20.463 INFO [stdout] test test_non_terminate_early ... ok
Dec 02 16:12:20.467 INFO [stdout] test test_symbol_relocation ... ok
Dec 02 16:12:20.467 INFO [stdout] test test_get_last_instruction_count ... ok
Dec 02 16:12:20.487 INFO [stdout] test test_load_elf ... ok
Dec 02 16:12:20.491 INFO [stdout] test test_vm_block_port ... ok
Dec 02 16:12:20.492 INFO [stdout] test test_verifier_success ... ok
Dec 02 16:12:20.529 INFO [stdout] test test_jit_call_helper_wo_verifier ... ok
Dec 02 16:12:20.535 INFO [stdout] test test_null_string ... ok
Dec 02 16:12:20.535 INFO [stdout] test test_load_elf_multiple_text ... ok
Dec 02 16:12:20.535 INFO [stdout] test test_vm_err_ldindb_nomem ... ok
Dec 02 16:12:20.535 INFO [stdout] test test_non_terminating ... ok
Dec 02 16:12:20.535 INFO [stdout] test test_verifier_fail ... ok
Dec 02 16:12:20.535 INFO [stdout] test test_vm_err_ldindb_oob ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_exec_no_program ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_jit_ldabsdw ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_jit_ldindb ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_jit_ldabsh ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_jit_ldabsw ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_jit_ldinddw ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_jit_ldindh ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_jit_ldindw ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_mbuff ... ok
Dec 02 16:12:20.536 INFO [stdout] test test_vm_mbuff_with_rust_api ... ok
Dec 02 16:12:20.539 INFO [stdout] test test_vm_jit_ldabsb ... ok
Dec 02 16:12:20.541 INFO [stdout] test test_vm_err_ldabsb_nomem ... ok
Dec 02 16:12:20.541 INFO [stdout] test test_vm_err_ldabsb_oob ... ok
Dec 02 16:12:20.541 INFO [stdout] test test_unterminated_string ... ok
Dec 02 16:12:20.541 INFO [stdout] 
Dec 02 16:12:20.541 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 16:12:20.541 INFO [stdout] 
Dec 02 16:12:20.543 INFO [stderr]      Running /target/debug/deps/ubpf_jit_x86_64-702e7fbd309ff5a9
Dec 02 16:12:20.545 INFO [stdout] 
Dec 02 16:12:20.545 INFO [stdout] running 97 tests
Dec 02 16:12:20.559 INFO [stdout] test test_jit_add ... ok
Dec 02 16:12:20.559 INFO [stdout] test test_jit_alu_bit ... ok
Dec 02 16:12:20.559 INFO [stdout] test test_jit_alu_arith ... ok
Dec 02 16:12:20.561 INFO [stdout] test test_jit_alu64_bit ... ok
Dec 02 16:12:20.561 INFO [stdout] test test_jit_arsh32_high_shift ... ok
Dec 02 16:12:20.562 INFO [stdout] test test_jit_alu64_arith ... ok
Dec 02 16:12:20.562 INFO [stdout] test test_jit_arsh ... ok
Dec 02 16:12:20.563 INFO [stdout] test test_jit_arsh64 ... ok
Dec 02 16:12:20.564 INFO [stdout] test test_jit_be64 ... ok
Dec 02 16:12:20.564 INFO [stdout] test test_jit_be32_high ... ok
Dec 02 16:12:20.565 INFO [stdout] test test_jit_be16 ... ok
Dec 02 16:12:20.570 INFO [stdout] test test_jit_arsh_reg ... ok
Dec 02 16:12:20.570 INFO [stdout] test test_jit_div64_imm ... ok
Dec 02 16:12:20.570 INFO [stdout] test test_jit_div32_high_divisor ... ok
Dec 02 16:12:20.583 INFO [stdout] test test_jit_be16_high ... ok
Dec 02 16:12:20.583 INFO [stdout] test test_jit_be32 ... ok
Dec 02 16:12:20.591 INFO [stdout] test test_jit_call ... ok
Dec 02 16:12:20.591 INFO [stdout] test test_jit_div32_imm ... ok
Dec 02 16:12:20.591 INFO [stdout] test test_jit_div32_reg ... ok
Dec 02 16:12:20.591 INFO [stdout] test test_jit_div64_reg ... ok
Dec 02 16:12:20.591 INFO [stdout] test test_jit_early_exit ... ok
Dec 02 16:12:20.592 INFO [stdout] test test_jit_call_memfrob ... ok
Dec 02 16:12:20.592 INFO [stdout] test test_jit_ja ... ok
Dec 02 16:12:20.592 INFO [stdout] test test_jit_exit ... ok
Dec 02 16:12:20.592 INFO [stdout] test test_jit_jgt_imm ... ok
Dec 02 16:12:20.592 INFO [stdout] test test_jit_jit_bounce ... ok
Dec 02 16:12:20.615 INFO [stdout] test test_jit_jle_imm ... ok
Dec 02 16:12:20.615 INFO [stdout] test test_jit_jlt_imm ... ok
Dec 02 16:12:20.615 INFO [stdout] test test_jit_jle_reg ... ok
Dec 02 16:12:20.615 INFO [stdout] test test_jit_jeq_imm ... ok
Dec 02 16:12:20.615 INFO [stdout] test test_jit_jge_imm ... ok
Dec 02 16:12:20.615 INFO [stdout] test test_jit_jeq_reg ... ok
Dec 02 16:12:20.615 INFO [stdout] test test_jit_jgt_reg ... ok
Dec 02 16:12:20.615 INFO [stdout] test test_jit_jlt_reg ... ok
Dec 02 16:12:20.615 INFO [stdout] test test_jit_jne_reg ... ok
Dec 02 16:12:20.631 INFO [stdout] test test_jit_jsge_reg ... ok
Dec 02 16:12:20.639 INFO [stdout] test test_jit_jsge_imm ... ok
Dec 02 16:12:20.639 INFO [stdout] test test_jit_jsgt_imm ... ok
Dec 02 16:12:20.639 INFO [stdout] test test_jit_jset_reg ... ok
Dec 02 16:12:20.651 INFO [stdout] test test_jit_lddw ... ok
Dec 02 16:12:20.654 INFO [stdout] test test_jit_jsgt_reg ... ok
Dec 02 16:12:20.654 INFO [stdout] test test_jit_jsle_imm ... ok
Dec 02 16:12:20.659 INFO [stdout] test test_jit_jslt_imm ... ok
Dec 02 16:12:20.671 INFO [stdout] test test_jit_jset_imm ... ok
Dec 02 16:12:20.671 INFO [stdout] test test_jit_jsle_reg ... ok
Dec 02 16:12:20.688 INFO [stdout] test test_jit_lddw2 ... ok
Dec 02 16:12:20.688 INFO [stdout] test test_jit_ldxb ... ok
Dec 02 16:12:20.688 INFO [stdout] test test_jit_ldxdw ... ok
Dec 02 16:12:20.689 INFO [stdout] test test_jit_jslt_reg ... ok
Dec 02 16:12:20.689 INFO [stdout] test test_jit_ldxb_all ... ok
Dec 02 16:12:20.708 INFO [stdout] test test_jit_ldxh ... ok
Dec 02 16:12:20.710 INFO [stdout] test test_jit_ldxh_all2 ... ok
Dec 02 16:12:20.711 INFO [stdout] test test_jit_le32 ... ok
Dec 02 16:12:20.711 INFO [stdout] test test_jit_le16 ... ok
Dec 02 16:12:20.717 INFO [stdout] test test_jit_ldxh_all ... ok
Dec 02 16:12:20.727 INFO [stdout] test test_jit_ldxh_same_reg ... ok
Dec 02 16:12:20.727 INFO [stdout] test test_jit_ldxw_all ... ok
Dec 02 16:12:20.727 INFO [stdout] test test_jit_err_call_unreg ... ok
Dec 02 16:12:20.727 INFO [stdout] test test_jit_ldxw ... ok
Dec 02 16:12:20.732 INFO [stdout] test test_jit_mod ... ok
Dec 02 16:12:20.736 INFO [stdout] test test_jit_mod32 ... ok
Dec 02 16:12:20.736 INFO [stdout] test test_jit_lsh_reg ... ok
Dec 02 16:12:20.736 INFO [stdout] test test_jit_le64 ... ok
Dec 02 16:12:20.739 INFO [stdout] test test_jit_mod64 ... ok
Dec 02 16:12:20.739 INFO [stdout] test test_jit_mul32_imm ... ok
Dec 02 16:12:20.739 INFO [stdout] test test_jit_mul32_reg ... ok
Dec 02 16:12:20.739 INFO [stdout] test test_jit_mul64_reg ... ok
Dec 02 16:12:20.754 INFO [stdout] test test_jit_mul32_reg_overflow ... ok
Dec 02 16:12:20.754 INFO [stdout] test test_jit_mov ... ok
Dec 02 16:12:20.754 INFO [stdout] test test_jit_mul64_imm ... ok
Dec 02 16:12:20.759 INFO [stdout] test test_jit_mul_loop ... ok
Dec 02 16:12:20.759 INFO [stdout] test test_jit_rhs32 ... ok
Dec 02 16:12:20.773 INFO [stdout] test test_jit_neg64 ... ok
Dec 02 16:12:20.773 INFO [stdout] test test_jit_neg ... ok
Dec 02 16:12:20.777 INFO [stdout] test test_jit_stack2 ... ok
Dec 02 16:12:20.777 INFO [stdout] test test_jit_stb ... ok
Dec 02 16:12:20.777 INFO [stdout] test test_jit_stdw ... ok
Dec 02 16:12:20.778 INFO [stdout] test test_jit_prime ... ok
Dec 02 16:12:20.778 INFO [stdout] test test_jit_rsh_reg ... ok
Dec 02 16:12:20.787 INFO [stdout] test test_jit_string_stack ... ok
Dec 02 16:12:20.787 INFO [stdout] test test_jit_stack ... ok
Dec 02 16:12:20.787 INFO [stdout] test test_jit_stxb_all2 ... ok
Dec 02 16:12:20.792 INFO [stdout] test test_jit_sth ... ok
Dec 02 16:12:20.792 INFO [stdout] test test_jit_stw ... ok
Dec 02 16:12:20.792 INFO [stdout] test test_jit_stxb ... ok
Dec 02 16:12:20.803 INFO [stdout] test test_jit_tcp_port80_match ... ok
Dec 02 16:12:20.819 INFO [stdout] test test_jit_stxb_all ... ok
Dec 02 16:12:20.819 INFO [stdout] test test_jit_tcp_port80_nomatch ... ok
Dec 02 16:12:20.819 INFO [stdout] test test_jit_stxw ... ok
Dec 02 16:12:20.819 INFO [stdout] test test_jit_tcp_port80_nomatch_ethertype ... ok
Dec 02 16:12:20.827 INFO [stdout] test test_jit_stxh ... ok
Dec 02 16:12:20.827 INFO [stdout] test test_jit_tcp_port80_nomatch_proto ... ok
Dec 02 16:12:20.827 INFO [stdout] test test_jit_stxb_chain ... ok
Dec 02 16:12:20.827 INFO [stdout] test test_jit_subnet ... ok
Dec 02 16:12:20.827 INFO [stdout] test test_jit_stxdw ... ok
Dec 02 16:12:20.831 INFO [stdout] test test_jit_tcp_sack_match ... ok
Dec 02 16:12:20.831 INFO [stdout] test test_jit_tcp_sack_nomatch ... ok
Dec 02 16:12:20.831 INFO [stdout] 
Dec 02 16:12:20.831 INFO [stdout] test result: ok. 97 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 16:12:20.831 INFO [stdout] 
Dec 02 16:12:20.839 INFO [stderr]      Running /target/debug/deps/ubpf_verifier-bbba066c72becd58
Dec 02 16:12:20.843 INFO [stdout] 
Dec 02 16:12:20.843 INFO [stdout] running 12 tests
Dec 02 16:12:20.939 INFO [stdout] test test_verifier_err_invalid_reg_dst ... ok
Dec 02 16:12:20.940 INFO [stdout] test test_verifier_err_jmp_out ... ok
Dec 02 16:12:20.940 INFO [stdout] test test_verifier_err_infinite_loop ... ok
Dec 02 16:12:20.940 INFO [stdout] test test_verifier_err_no_exit ... ok
Dec 02 16:12:20.941 INFO [stdout] test test_verifier_err_div_by_zero_imm ... ok
Dec 02 16:12:20.941 INFO [stdout] test test_verifier_err_invalid_reg_src ... ok
Dec 02 16:12:20.941 INFO [stdout] test test_verifier_err_jmp_lddw ... ok
Dec 02 16:12:20.941 INFO [stdout] test test_verifier_err_endian_size ... ok
Dec 02 16:12:20.941 INFO [stdout] test test_verifier_err_incomplete_lddw ... ok
Dec 02 16:12:20.943 INFO [stdout] test test_verifier_err_write_r10 ... ok
Dec 02 16:12:20.951 INFO [stdout] test test_verifier_err_unknown_opcode ... ok
Dec 02 16:12:20.951 INFO [stdout] test test_verifier_err_too_many_instructions ... ok
Dec 02 16:12:20.951 INFO [stdout] 
Dec 02 16:12:20.951 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 16:12:20.951 INFO [stdout] 
Dec 02 16:12:20.953 INFO [stderr]      Running /target/debug/deps/ubpf_vm-962a047a32123925
Dec 02 16:12:20.955 INFO [stdout] 
Dec 02 16:12:20.955 INFO [stdout] running 102 tests
Dec 02 16:12:20.960 INFO [stdout] test test_vm_add ... ok
Dec 02 16:12:20.961 INFO [stdout] test test_vm_arsh32_high_shift ... ok
Dec 02 16:12:20.961 INFO [stdout] test test_vm_arsh64 ... ok
Dec 02 16:12:20.962 INFO [stdout] test test_vm_alu64_bit ... ok
Dec 02 16:12:20.963 INFO [stdout] test test_vm_arsh ... ok
Dec 02 16:12:20.965 INFO [stdout] test test_vm_arsh_reg ... ok
Dec 02 16:12:20.965 INFO [stdout] test test_vm_alu64_arith ... ok
Dec 02 16:12:20.977 INFO [stdout] test test_vm_be16_high ... ok
Dec 02 16:12:20.977 INFO [stdout] test test_vm_be32 ... ok
Dec 02 16:12:20.977 INFO [stdout] test test_vm_be32_high ... ok
Dec 02 16:12:20.983 INFO [stdout] test test_vm_alu_arith ... ok
Dec 02 16:12:20.983 INFO [stdout] test test_vm_alu_bit ... ok
Dec 02 16:12:20.983 INFO [stdout] test test_vm_call ... ok
Dec 02 16:12:20.983 INFO [stdout] test test_vm_div32_high_divisor ... ok
Dec 02 16:12:20.983 INFO [stdout] test test_vm_be16 ... ok
Dec 02 16:12:20.983 INFO [stdout] test test_vm_be64 ... ok
Dec 02 16:12:20.984 INFO [stdout] test test_vm_call_memfrob ... ok
Dec 02 16:12:20.984 INFO [stdout] test test_vm_div32_imm ... ok
Dec 02 16:12:20.991 INFO [stdout] test test_vm_div64_imm ... ok
Dec 02 16:12:20.991 INFO [stdout] test test_vm_div64_reg ... ok
Dec 02 16:12:21.009 INFO [stdout] test test_vm_div32_reg ... ok
Dec 02 16:12:21.011 INFO [stdout] test test_vm_early_exit ... ok
Dec 02 16:12:21.015 INFO [stdout] test test_vm_exit ... ok
Dec 02 16:12:21.015 INFO [stdout] test test_vm_ja ... ok
Dec 02 16:12:21.031 INFO [stdout] test test_vm_jeq_imm ... ok
Dec 02 16:12:21.031 INFO [stdout] test test_vm_jeq_reg ... ok
Dec 02 16:12:21.053 INFO [stdout] test test_vm_jgt_imm ... ok
Dec 02 16:12:21.053 INFO [stdout] test test_vm_jge_imm ... ok
Dec 02 16:12:21.053 INFO [stdout] test test_vm_jgt_reg ... ok
Dec 02 16:12:21.054 INFO [stdout] test test_vm_jit_bounce ... ok
Dec 02 16:12:21.055 INFO [stdout] test test_vm_jle_imm ... ok
Dec 02 16:12:21.060 INFO [stdout] test test_vm_jle_reg ... ok
Dec 02 16:12:21.060 INFO [stdout] test test_vm_jlt_imm ... ok
Dec 02 16:12:21.061 INFO [stdout] test test_vm_jlt_reg ... ok
Dec 02 16:12:21.062 INFO [stdout] test test_vm_jne_reg ... ok
Dec 02 16:12:21.072 INFO [stdout] test test_vm_jset_imm ... ok
Dec 02 16:12:21.076 INFO [stdout] test test_vm_jsge_imm ... ok
Dec 02 16:12:21.084 INFO [stdout] test test_vm_jset_reg ... ok
Dec 02 16:12:21.084 INFO [stdout] test test_vm_jsge_reg ... ok
Dec 02 16:12:21.084 INFO [stdout] test test_vm_jsgt_imm ... ok
Dec 02 16:12:21.085 INFO [stdout] test test_vm_jsgt_reg ... ok
Dec 02 16:12:21.095 INFO [stdout] test test_vm_err_call_unreg ... ok
Dec 02 16:12:21.099 INFO [stdout] test test_vm_jsle_reg ... ok
Dec 02 16:12:21.099 INFO [stdout] test test_vm_err_div64_by_zero_reg ... ok
Dec 02 16:12:21.107 INFO [stdout] test test_vm_err_div_by_zero_reg ... ok
Dec 02 16:12:21.111 INFO [stdout] test test_vm_jsle_imm ... ok
Dec 02 16:12:21.119 INFO [stdout] test test_vm_err_mod64_by_zero_reg ... ok
Dec 02 16:12:21.125 INFO [stdout] test test_vm_jslt_imm ... ok
Dec 02 16:12:21.126 INFO [stdout] test test_vm_lddw ... ok
Dec 02 16:12:21.131 INFO [stdout] test test_vm_jslt_reg ... ok
Dec 02 16:12:21.131 INFO [stdout] test test_vm_err_stack_out_of_bound ... ok
Dec 02 16:12:21.139 INFO [stdout] test test_vm_err_mod_by_zero_reg ... ok
Dec 02 16:12:21.140 INFO [stdout] test test_vm_lddw2 ... ok
Dec 02 16:12:21.148 INFO [stdout] test test_vm_ldxb ... ok
Dec 02 16:12:21.152 INFO [stdout] test test_vm_ldxdw ... ok
Dec 02 16:12:21.152 INFO [stdout] test test_vm_ldxh_same_reg ... ok
Dec 02 16:12:21.152 INFO [stdout] test test_vm_ldxh ... ok
Dec 02 16:12:21.160 INFO [stdout] test test_vm_ldxw_all ... ok
Dec 02 16:12:21.160 INFO [stdout] test test_vm_ldxh_all2 ... ok
Dec 02 16:12:21.161 INFO [stdout] test test_vm_ldxb_all ... ok
Dec 02 16:12:21.161 INFO [stdout] test test_vm_ldxh_all ... ok
Dec 02 16:12:21.168 INFO [stdout] test test_vm_mod32 ... ok
Dec 02 16:12:21.168 INFO [stdout] test test_vm_le32 ... ok
Dec 02 16:12:21.175 INFO [stdout] test test_vm_ldxw ... ok
Dec 02 16:12:21.176 INFO [stdout] test test_vm_lsh_reg ... ok
Dec 02 16:12:21.177 INFO [stdout] test test_vm_mod ... ok
Dec 02 16:12:21.178 INFO [stdout] test test_vm_le16 ... ok
Dec 02 16:12:21.178 INFO [stdout] test test_vm_le64 ... ok
Dec 02 16:12:21.179 INFO [stdout] test test_vm_mod64 ... ok
Dec 02 16:12:21.180 INFO [stdout] test test_vm_mov ... ok
Dec 02 16:12:21.180 INFO [stdout] test test_vm_mul32_imm ... ok
Dec 02 16:12:21.181 INFO [stdout] test test_vm_mul32_reg ... ok
Dec 02 16:12:21.182 INFO [stdout] test test_vm_mul32_reg_overflow ... ok
Dec 02 16:12:21.182 INFO [stdout] test test_vm_mul64_imm ... ok
Dec 02 16:12:21.183 INFO [stdout] test test_vm_mul64_reg ... ok
Dec 02 16:12:21.184 INFO [stdout] test test_vm_mul_loop ... ok
Dec 02 16:12:21.185 INFO [stdout] test test_vm_neg ... ok
Dec 02 16:12:21.185 INFO [stdout] test test_vm_neg64 ... ok
Dec 02 16:12:21.186 INFO [stdout] test test_vm_prime ... ok
Dec 02 16:12:21.187 INFO [stdout] test test_vm_rhs32 ... ok
Dec 02 16:12:21.188 INFO [stdout] test test_vm_rsh_reg ... ok
Dec 02 16:12:21.188 INFO [stdout] test test_vm_stack2 ... ok
Dec 02 16:12:21.189 INFO [stdout] test test_vm_stack ... ok
Dec 02 16:12:21.189 INFO [stdout] test test_vm_stb ... ok
Dec 02 16:12:21.190 INFO [stdout] test test_vm_stdw ... ok
Dec 02 16:12:21.191 INFO [stdout] test test_vm_sth ... ok
Dec 02 16:12:21.199 INFO [stdout] test test_vm_string_stack ... ok
Dec 02 16:12:21.199 INFO [stdout] test test_vm_stw ... ok
Dec 02 16:12:21.200 INFO [stdout] test test_vm_stxb ... ok
Dec 02 16:12:21.201 INFO [stdout] test test_vm_stxb_all ... ok
Dec 02 16:12:21.202 INFO [stdout] test test_vm_stxb_all2 ... ok
Dec 02 16:12:21.204 INFO [stdout] test test_vm_stxb_chain ... ok
Dec 02 16:12:21.204 INFO [stdout] test test_vm_stxw ... ok
Dec 02 16:12:21.205 INFO [stdout] test test_vm_stxdw ... ok
Dec 02 16:12:21.206 INFO [stdout] test test_vm_stxh ... ok
Dec 02 16:12:21.219 INFO [stdout] test test_vm_subnet ... ok
Dec 02 16:12:21.219 INFO [stdout] test test_vm_tcp_port80_match ... ok
Dec 02 16:12:21.219 INFO [stdout] test test_vm_tcp_sack_nomatch ... ok
Dec 02 16:12:21.219 INFO [stdout] test test_vm_tcp_port80_nomatch ... ok
Dec 02 16:12:21.219 INFO [stdout] test test_vm_tcp_port80_nomatch_ethertype ... ok
Dec 02 16:12:21.221 INFO [stdout] test test_vm_tcp_port80_nomatch_proto ... ok
Dec 02 16:12:21.221 INFO [stdout] test test_vm_tcp_sack_match ... ok
Dec 02 16:12:21.221 INFO [stdout] 
Dec 02 16:12:21.221 INFO [stdout] test result: ok. 102 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 16:12:21.221 INFO [stdout] 
Dec 02 16:12:21.231 INFO [stderr]    Doc-tests solana_rbpf
Dec 02 16:12:25.023 INFO [stdout] 
Dec 02 16:12:25.023 INFO [stdout] running 55 tests
Dec 02 16:12:47.955 INFO [stdout] test src/disassembler.rs - disassembler::disassemble (line 323) ... ok
Dec 02 16:12:49.387 INFO [stdout] test src/ebpf.rs - ebpf::get_insn (line 520) ... ok
Dec 02 16:12:51.459 INFO [stdout] test src/ebpf.rs - ebpf::Insn::to_array (line 436) ... ok
Dec 02 16:12:51.691 INFO [stdout] test src/ebpf.rs - ebpf::Insn::to_vec (line 468) ... ok
Dec 02 16:12:53.603 INFO [stdout] test src/disassembler.rs - disassembler::to_insn_vec (line 122) ... ok
Dec 02 16:12:54.811 INFO [stdout] test src/ebpf.rs - ebpf::get_insn (line 507) ... ok
Dec 02 16:12:55.103 INFO [stdout] test src/ebpf.rs - ebpf::to_insn_vec (line 556) ... ok
Dec 02 16:12:55.728 INFO [stdout] test src/assembler.rs - assembler::assemble (line 210) ... ok
Dec 02 16:13:13.823 INFO [stdout] test src/helpers.rs - helpers::bpf_trace_printf (line 72) ... ok
Dec 02 16:13:14.307 INFO [stdout] test src/helpers.rs - helpers::memfrob (line 142) ... ok
Dec 02 16:13:14.399 INFO [stdout] test src/helpers.rs - helpers::gather_bytes (line 122) ... ok
Dec 02 16:13:15.560 INFO [stdout] test src/helpers.rs - helpers::bpf_time_getns (line 41) ... ok
Dec 02 16:13:16.525 INFO [stdout] test src/helpers.rs - helpers::rand (line 251) ... ok
Dec 02 16:13:18.341 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff (line 881) ... ok
Dec 02 16:13:18.899 INFO [stdout] test src/helpers.rs - helpers::strcmp (line 206) ... ok
Dec 02 16:13:18.912 INFO [stdout] test src/helpers.rs - helpers::sqrti (line 190) ... ok
Dec 02 16:13:31.326 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::execute_program (line 1168) ... ok
Dec 02 16:13:31.403 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::execute_program_jit (line 1262) ... ok
Dec 02 16:13:31.485 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::get_last_instruction_count (line 1058) ... ok
Dec 02 16:13:32.382 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::jit_compile (line 1208) ... ok
Dec 02 16:13:34.219 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::set_program (line 962) ... ok
Dec 02 16:13:34.427 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::new (line 926) ... ok
Dec 02 16:13:35.151 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::set_max_instruction_count (line 1036) ... ok
Dec 02 16:13:37.134 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::register_helper (line 1091) ... ok
Dec 02 16:13:48.619 INFO [stdout] test src/lib.rs - EbpfVmMbuff (line 73) ... ok
Dec 02 16:13:49.744 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::execute_program_jit (line 794) ... ok
Dec 02 16:13:49.845 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::execute_program (line 359) ... ok
Dec 02 16:13:50.183 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::set_verifier (line 1003) ... ok
Dec 02 16:13:50.459 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::jit_compile (line 744) ... ok
Dec 02 16:13:50.471 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::get_last_instruction_count (line 244) ... ok
Dec 02 16:13:50.991 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::register_helper (line 287) ... ok
Dec 02 16:13:51.939 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::new (line 117) ... ok
Dec 02 16:14:03.647 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::get_last_instruction_count (line 1828) ... ok
Dec 02 16:14:06.264 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::set_max_instruction_count (line 221) ... ok
Dec 02 16:14:07.411 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::set_program (line 147) ... ok
Dec 02 16:14:08.331 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::execute_program_jit (line 1971) ... ok
Dec 02 16:14:08.819 INFO [stdout] test src/lib.rs - EbpfVmNoData (line 1669) ... ok
Dec 02 16:14:09.109 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::set_verifier (line 182) ... ok
Dec 02 16:14:09.123 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::execute_program (line 1940) ... ok
Dec 02 16:14:09.944 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::jit_compile (line 1920) ... ok
Dec 02 16:14:25.739 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::new (line 1714) ... ok
Dec 02 16:14:28.173 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::register_helper (line 1857) ... ok
Dec 02 16:14:29.147 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::set_max_instruction_count (line 1806) ... ok
Dec 02 16:14:29.887 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::set_program (line 1735) ... ok
Dec 02 16:14:30.907 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::execute_program_jit (line 1635) ... ok
Dec 02 16:14:31.132 INFO [stdout] test src/lib.rs - EbpfVmRaw (line 1319) ... ok
Dec 02 16:14:31.431 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::execute_program (line 1562) ... ok
Dec 02 16:14:31.823 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::set_verifier (line 1773) ... ok
Dec 02 16:14:41.051 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::get_last_instruction_count (line 1464) ... ok
Dec 02 16:14:44.671 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::jit_compile (line 1590) ... ok
Dec 02 16:14:45.091 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::new (line 1348) ... ok
Dec 02 16:14:45.306 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::set_program (line 1370) ... ok
Dec 02 16:14:45.748 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::register_helper (line 1497) ... ok
Dec 02 16:14:45.999 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::set_max_instruction_count (line 1442) ... ok
Dec 02 16:14:46.151 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::set_verifier (line 1409) ... ok
Dec 02 16:14:46.151 INFO [stdout] 
Dec 02 16:14:46.152 INFO [stdout] test result: ok. 55 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 16:14:46.152 INFO [stdout] 
Dec 02 16:14:46.173 INFO [stderr] su: No module specific data is present
Dec 02 16:14:47.027 INFO running `"docker" "inspect" "bdf623c5cc8d8365b6e03bd6d770a93bd213f706f039a2875d989b466a6939d0"`
Dec 02 16:14:47.339 INFO running `"docker" "rm" "-f" "bdf623c5cc8d8365b6e03bd6d770a93bd213f706f039a2875d989b466a6939d0"`
Dec 02 16:14:47.575 INFO [stdout] bdf623c5cc8d8365b6e03bd6d770a93bd213f706f039a2875d989b466a6939d0
